Dec 03 18:11:58.347 INFO testing bip_utracker-0.4.0 against master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61 for beta-1.31-5
Dec 03 18:11:58.347 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 18:11:58.611 INFO [stdout] 5ad736af475bacf771c90ffcadc635087ff541e2c7e14f07f3a82d81a74ae041
Dec 03 18:11:58.615 INFO running `"docker" "start" "-a" "5ad736af475bacf771c90ffcadc635087ff541e2c7e14f07f3a82d81a74ae041"`
Dec 03 18:11:59.522 INFO [stderr] usermod: no changes
Dec 03 18:11:59.811 INFO [stderr]    Compiling miow v0.1.5
Dec 03 18:11:59.823 INFO [stderr]    Compiling chrono v0.2.25
Dec 03 18:12:00.847 INFO [stderr]    Compiling mio v0.5.1
Dec 03 18:12:04.687 INFO [stderr]    Compiling umio v0.3.0
Dec 03 18:12:06.027 INFO [stderr]    Compiling bip_util v0.5.0
Dec 03 18:12:09.223 INFO [stderr]    Compiling bip_handshake v0.7.1
Dec 03 18:12:15.675 INFO [stderr]    Compiling bip_utracker v0.4.0 (/source)
Dec 03 18:12:23.547 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.97s
Dec 03 18:12:23.555 INFO [stderr] su: No module specific data is present
Dec 03 18:12:24.183 INFO running `"docker" "inspect" "5ad736af475bacf771c90ffcadc635087ff541e2c7e14f07f3a82d81a74ae041"`
Dec 03 18:12:24.462 INFO running `"docker" "rm" "-f" "5ad736af475bacf771c90ffcadc635087ff541e2c7e14f07f3a82d81a74ae041"`
Dec 03 18:12:24.767 INFO [stdout] 5ad736af475bacf771c90ffcadc635087ff541e2c7e14f07f3a82d81a74ae041
Dec 03 18:12:24.773 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 18:12:25.288 INFO [stdout] 30b02e3bf791dd4356eeb6720ba0343e25a5e5ca35b7a28077fdeccff37893f2
Dec 03 18:12:25.291 INFO running `"docker" "start" "-a" "30b02e3bf791dd4356eeb6720ba0343e25a5e5ca35b7a28077fdeccff37893f2"`
Dec 03 18:12:26.850 INFO [stderr] usermod: no changes
Dec 03 18:12:27.055 INFO [stderr]    Compiling bip_utracker v0.4.0 (/source)
Dec 03 18:12:45.623 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.74s
Dec 03 18:12:45.635 INFO [stderr] su: No module specific data is present
Dec 03 18:12:46.412 INFO running `"docker" "inspect" "30b02e3bf791dd4356eeb6720ba0343e25a5e5ca35b7a28077fdeccff37893f2"`
Dec 03 18:12:46.885 INFO running `"docker" "rm" "-f" "30b02e3bf791dd4356eeb6720ba0343e25a5e5ca35b7a28077fdeccff37893f2"`
Dec 03 18:12:47.183 INFO [stdout] 30b02e3bf791dd4356eeb6720ba0343e25a5e5ca35b7a28077fdeccff37893f2
Dec 03 18:12:47.185 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 18:12:47.684 INFO [stdout] 9a7be5f01d73807347a1ec3f2797e5b1b5c8cf52d536a577f692f3cfe0364306
Dec 03 18:12:47.687 INFO running `"docker" "start" "-a" "9a7be5f01d73807347a1ec3f2797e5b1b5c8cf52d536a577f692f3cfe0364306"`
Dec 03 18:12:49.131 INFO [stderr] usermod: no changes
Dec 03 18:12:49.339 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.19s
Dec 03 18:12:49.356 INFO [stderr]      Running /target/debug/deps/bip_utracker-3d96cc2e55e0ae13
Dec 03 18:12:49.376 INFO [stdout] 
Dec 03 18:12:49.376 INFO [stdout] running 76 tests
Dec 03 18:12:49.395 INFO [stdout] test announce::tests::negative_parse_empty_v4_source ... ok
Dec 03 18:12:49.395 INFO [stdout] test announce::tests::negative_parse_incomplete_state ... ok
Dec 03 18:12:49.395 INFO [stdout] test announce::tests::positive_parse_desired_peers_specified ... ok
Dec 03 18:12:49.395 INFO [stdout] test announce::tests::positive_parse_completed_event ... ok
Dec 03 18:12:49.395 INFO [stdout] test announce::tests::positive_parse_desired_peers_default ... ok
Dec 03 18:12:49.395 INFO [stdout] test announce::tests::negative_parse_request_missing_key ... ok
Dec 03 18:12:49.395 INFO [stdout] test announce::tests::negative_parse_incomplete_v6_source ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::negative_parse_empty_v6_source ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::negative_parse_incomplete_v4_source ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::negative_parse_no_event ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_explicit_v4_source ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_explicit_v6_source ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_implied_v6_source ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_implied_v4_source ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_stopped_event ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_write_completed_event ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_state ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_write_desired_peers_specified ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_started_event ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_response_many_peers ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_response_empty_peers ... ok
Dec 03 18:12:49.415 INFO [stdout] test announce::tests::positive_parse_none_event ... ok
Dec 03 18:12:49.416 INFO [stdout] test announce::tests::positive_parse_request_empty_options ... ok
Dec 03 18:12:49.416 INFO [stdout] test announce::tests::positive_write_desired_peers_default ... ok
Dec 03 18:12:49.416 INFO [stdout] test announce::tests::positive_write_response ... ok
Dec 03 18:12:49.416 INFO [stdout] test announce::tests::positive_write_source_ipv4_explicit ... ok
Dec 03 18:12:49.416 INFO [stdout] test announce::tests::positive_write_source_ipv4_implied ... ok
Dec 03 18:12:49.416 INFO [stdout] test announce::tests::positive_write_source_ipv6_explicit ... ok
Dec 03 18:12:49.416 INFO [stdout] test announce::tests::positive_write_state ... ok
Dec 03 18:12:49.416 INFO [stdout] test announce::tests::positive_write_started_event ... ok
Dec 03 18:12:49.417 INFO [stdout] test announce::tests::positive_write_source_ipv6_implied ... ok
Dec 03 18:12:49.417 INFO [stdout] test announce::tests::positive_write_stopped_event ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_iterate_v6 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_iterate_v4 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_parse_empty_v4 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_parse_empty_v6 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_parse_peer_v6 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_parse_peer_v4 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_parse_peers_v6 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_parse_peers_v4 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_write_empty_v4 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_write_empty_v6 ... ok
Dec 03 18:12:49.417 INFO [stdout] test contact::tests::positive_write_peer_v4 ... ok
Dec 03 18:12:49.418 INFO [stdout] test contact::tests::positive_write_peer_v6 ... ok
Dec 03 18:12:49.418 INFO [stdout] test contact::tests::positive_write_peers_v6 ... ok
Dec 03 18:12:49.418 INFO [stdout] test option::tests::negative_parse_url_data_incomplete ... ok
Dec 03 18:12:49.418 INFO [stdout] test option::tests::negative_parse_url_data_unterminated ... ok
Dec 03 18:12:49.418 INFO [stdout] test contact::tests::positive_write_peers_v4 ... ok
Dec 03 18:12:49.418 INFO [stdout] test option::tests::positive_parse_empty_option ... ok
Dec 03 18:12:49.418 INFO [stdout] test option::tests::positive_parse_end_option ... ok
Dec 03 18:12:49.418 INFO [stdout] test option::tests::positive_parse_noop_option ... ok
Dec 03 18:12:49.418 INFO [stdout] test option::tests::positive_parse_url_data_single_chunk ... ok
Dec 03 18:12:49.419 INFO [stdout] test option::tests::positive_parse_url_data_noop_end_of_options ... ok
Dec 03 18:12:49.419 INFO [stdout] test option::tests::positive_parse_url_data_noop_eof ... ok
Dec 03 18:12:49.419 INFO [stdout] test option::tests::positive_parse_url_data_end_of_options ... ok
Dec 03 18:12:49.419 INFO [stdout] test option::tests::positive_pasre_url_data_eof ... ok
Dec 03 18:12:49.419 INFO [stdout] test option::tests::positive_parse_url_data_two_chunks ... ok
Dec 03 18:12:49.419 INFO [stdout] test option::tests::positive_parse_url_data_undivisible_chunks ... ok
Dec 03 18:12:49.419 INFO [stdout] test option::tests::positive_write_chunked_option ... ok
Dec 03 18:12:49.420 INFO [stdout] test option::tests::positive_write_empty_option ... ok
Dec 03 18:12:49.420 INFO [stdout] test option::tests::positive_write_eof_option ... ok
Dec 03 18:12:49.420 INFO [stdout] test option::tests::positive_write_single_option ... ok
Dec 03 18:12:49.420 INFO [stdout] test scrape::tests::positive_parse_request_empty ... ok
Dec 03 18:12:49.420 INFO [stdout] test announce::tests::positive_write_request ... ok
Dec 03 18:12:49.420 INFO [stdout] test announce::tests::positive_write_none_event ... ok
Dec 03 18:12:49.421 INFO [stdout] test scrape::tests::positive_parse_request_single_hash ... ok
Dec 03 18:12:49.421 INFO [stdout] test scrape::tests::positive_parse_request_multiple_hashes ... ok
Dec 03 18:12:49.421 INFO [stdout] test scrape::tests::positive_write_request_many_hashes ... ok
Dec 03 18:12:49.421 INFO [stdout] test scrape::tests::positive_write_request_single_hash ... ok
Dec 03 18:12:49.421 INFO [stdout] test scrape::tests::positive_parse_response_many_stats ... ok
Dec 03 18:12:49.421 INFO [stdout] test scrape::tests::positive_parse_response_empty ... ok
Dec 03 18:12:49.422 INFO [stdout] test scrape::tests::positive_write_response_empty ... ok
Dec 03 18:12:49.427 INFO [stdout] test scrape::tests::positive_parse_response_single_stat ... ok
Dec 03 18:12:49.427 INFO [stdout] test scrape::tests::positive_write_request_empty ... ok
Dec 03 18:12:49.427 INFO [stdout] test scrape::tests::positive_write_response_many_stats ... ok
Dec 03 18:12:49.427 INFO [stdout] test scrape::tests::positive_write_response_single_stat ... ok
Dec 03 18:12:49.427 INFO [stdout] 
Dec 03 18:12:49.428 INFO [stdout] test result: ok. 76 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 18:12:49.428 INFO [stdout] 
Dec 03 18:12:49.429 INFO [stderr]      Running /target/debug/deps/test-b7213f0b9a656128
Dec 03 18:12:49.436 INFO [stdout] 
Dec 03 18:12:49.436 INFO [stdout] running 8 tests
Dec 03 18:12:49.447 INFO [stdout] test test_client_drop::positive_client_request_failed ... ok
Dec 03 18:12:49.467 INFO [stdout] test test_client_full::positive_client_request_dropped ... ok
Dec 03 18:12:49.546 INFO [stdout] test test_scrape::positive_scrape ... ok
Dec 03 18:12:49.595 INFO [stdout] test test_announce_start::positive_announce_started ... ok
Dec 03 18:12:49.595 INFO [stdout] test test_connect::positive_receive_connect_id ... ok
Dec 03 18:12:49.596 INFO [stdout] test test_connect_cache::positive_connection_id_cache ... ok
Dec 03 18:12:49.596 INFO [stdout] test test_announce_stop::positive_announce_stopped ... ok
Dec 03 18:12:49.639 INFO [stdout] test test_server_drop::positive_server_dropped ... ok
Dec 03 18:12:49.639 INFO [stdout] 
Dec 03 18:12:49.639 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 18:12:49.639 INFO [stdout] 
Dec 03 18:12:49.640 INFO [stderr]    Doc-tests bip_utracker
Dec 03 18:13:01.669 INFO [stdout] 
Dec 03 18:13:01.669 INFO [stdout] running 0 tests
Dec 03 18:13:01.669 INFO [stdout] 
Dec 03 18:13:01.669 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 18:13:01.669 INFO [stdout] 
Dec 03 18:13:01.682 INFO [stderr] su: No module specific data is present
Dec 03 18:13:02.178 INFO running `"docker" "inspect" "9a7be5f01d73807347a1ec3f2797e5b1b5c8cf52d536a577f692f3cfe0364306"`
Dec 03 18:13:02.309 INFO running `"docker" "rm" "-f" "9a7be5f01d73807347a1ec3f2797e5b1b5c8cf52d536a577f692f3cfe0364306"`
Dec 03 18:13:02.451 INFO [stdout] 9a7be5f01d73807347a1ec3f2797e5b1b5c8cf52d536a577f692f3cfe0364306
